[INFO] cloning repository https://github.com/ivanbgd/redis-server-rust
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ivanbgd/redis-server-rust" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fivanbgd%2Fredis-server-rust", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fivanbgd%2Fredis-server-rust'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 612fa5df60acb22c946665bc5ad1a1c1050b52b1
[INFO] testing ivanbgd/redis-server-rust against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fivanbgd%2Fredis-server-rust" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/ivanbgd/redis-server-rust
[INFO] finished tweaking git repo https://github.com/ivanbgd/redis-server-rust
[INFO] tweaked toml for git repo https://github.com/ivanbgd/redis-server-rust written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/ivanbgd/redis-server-rust on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/ivanbgd/redis-server-rust already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded env_logger v0.11.7
[INFO] [stderr]   Downloaded jiff-static v0.2.4
[INFO] [stderr]   Downloaded jiff v0.2.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 80cc2fb270f50bc496f7882004eff26438869c08da8a723b9d4f07a1624b0741
[INFO] running `Command { std: "docker" "start" "-a" "80cc2fb270f50bc496f7882004eff26438869c08da8a723b9d4f07a1624b0741", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "80cc2fb270f50bc496f7882004eff26438869c08da8a723b9d4f07a1624b0741", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "80cc2fb270f50bc496f7882004eff26438869c08da8a723b9d4f07a1624b0741", kill_on_drop: false }`
[INFO] [stdout] 80cc2fb270f50bc496f7882004eff26438869c08da8a723b9d4f07a1624b0741
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 896ff4aabf7a7db5e6bf39c8daf7aa0c1014dd2e3e6c91759f6a59af1fac3aa0
[INFO] running `Command { std: "docker" "start" "-a" "896ff4aabf7a7db5e6bf39c8daf7aa0c1014dd2e3e6c91759f6a59af1fac3aa0", kill_on_drop: false }`
[INFO] [stderr]    Compiling anstyle v1.0.10
[INFO] [stderr]    Compiling anstyle-query v1.1.2
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling colorchoice v1.0.3
[INFO] [stderr]    Compiling smallvec v1.14.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.6
[INFO] [stderr]    Compiling clap_lex v0.7.4
[INFO] [stderr]    Compiling anyhow v1.0.97
[INFO] [stderr]    Compiling jiff v0.2.4
[INFO] [stderr]    Compiling syn v2.0.100
[INFO] [stderr]    Compiling signal-hook-registry v1.4.2
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling anstream v0.6.18
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling clap_builder v4.5.32
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling thiserror-impl v2.0.12
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling clap_derive v4.5.32
[INFO] [stderr]    Compiling tokio v1.44.1
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling thiserror v2.0.12
[INFO] [stderr]    Compiling env_filter v0.1.3
[INFO] [stderr]    Compiling env_logger v0.11.7
[INFO] [stderr]    Compiling clap v4.5.32
[INFO] [stderr]    Compiling redis-server v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `crate::log_and_stderr`
[INFO] [stdout]  --> src/server.rs:8:5
[INFO] [stdout]   |
[INFO] [stdout] 8 | use crate::log_and_stderr;
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 29.31s
[INFO] running `Command { std: "docker" "inspect" "896ff4aabf7a7db5e6bf39c8daf7aa0c1014dd2e3e6c91759f6a59af1fac3aa0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "896ff4aabf7a7db5e6bf39c8daf7aa0c1014dd2e3e6c91759f6a59af1fac3aa0", kill_on_drop: false }`
[INFO] [stdout] 896ff4aabf7a7db5e6bf39c8daf7aa0c1014dd2e3e6c91759f6a59af1fac3aa0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1054d6035e621cd66881b7277889c282aba78d06668b84e97493793f42e1e8af
[INFO] running `Command { std: "docker" "start" "-a" "1054d6035e621cd66881b7277889c282aba78d06668b84e97493793f42e1e8af", kill_on_drop: false }`
[INFO] [stderr]    Compiling redis-server v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `crate::log_and_stderr`
[INFO] [stdout]  --> src/server.rs:8:5
[INFO] [stdout]   |
[INFO] [stdout] 8 | use crate::log_and_stderr;
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `crate::log_and_stderr`
[INFO] [stdout]  --> src/server.rs:8:5
[INFO] [stdout]   |
[INFO] [stdout] 8 | use crate::log_and_stderr;
[INFO] [stdout]   |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.68s
[INFO] running `Command { std: "docker" "inspect" "1054d6035e621cd66881b7277889c282aba78d06668b84e97493793f42e1e8af", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1054d6035e621cd66881b7277889c282aba78d06668b84e97493793f42e1e8af", kill_on_drop: false }`
[INFO] [stdout] 1054d6035e621cd66881b7277889c282aba78d06668b84e97493793f42e1e8af
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5e1f236c4d2bd5a44e6c05a594253a5694f2cf18d82374f5fef057aa28706156
[INFO] running `Command { std: "docker" "start" "-a" "5e1f236c4d2bd5a44e6c05a594253a5694f2cf18d82374f5fef057aa28706156", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `crate::log_and_stderr`
[INFO] [stdout] 
[INFO] [stderr]  --> src/server.rs:8:5
[INFO] [stdout] running 46 tests
[INFO] [stderr]   |
[INFO] [stdout] test cmd::tests::handle_ping_ping_pong ... ok
[INFO] [stderr] 8 | use crate::log_and_stderr;
[INFO] [stdout] test cmd::tests::handle_request_ping_arg_echo_ping ... ok
[INFO] [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^
[INFO] [stdout] test cmd::tests::handle_request_ping_echo_ping_arg ... ok
[INFO] [stderr]   |
[INFO] [stdout] test cmd::tests::handle_request_ping_pong_pass ... ok
[INFO] [stderr]   = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] test cmd::tests::handle_request_ping_ping_ping ... ok
[INFO] [stderr] 
[INFO] [stdout] test cmd::tests::handle_request_echo_hey ... ok
[INFO] [stderr] warning: `redis-server` (lib) generated 1 warning (run `cargo fix --lib -p redis-server` to apply 1 suggestion)
[INFO] [stdout] test cmd::tests::handle_request_ping_pong_fail_missing_array_len ... ok
[INFO] [stderr] warning: `redis-server` (lib test) generated 1 warning (1 duplicate)
[INFO] [stdout] test cmd::tests::handle_request_echo_hey_hey ... ok
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stdout] test cmd::tests::handle_request_ping_with_arg ... ok
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/redis_server-a39672afb6ed6d95)
[INFO] [stdout] test cmd::tests::handle_request_set_01_get ... ok
[INFO] [stdout] test cmd::tests::handle_request_ping_pong_missing_crlf_at_end ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_ping ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_empty ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_nested ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_mixed_data_types ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_null ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_integers ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_echo ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_ping_with_arg ... ok
[INFO] [stdout] test resp::tests::test_deserialize_bulk_string_empty ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_two_elts ... ok
[INFO] [stdout] test resp::tests::test_deserialize_bulk_string_hello ... ok
[INFO] [stdout] test resp::tests::test_deserialize_bulk_string_null ... ok
[INFO] [stdout] test resp::tests::test_deserialize_integer_plus_thousand ... ok
[INFO] [stdout] test resp::tests::test_deserialize_integer_negative_thousand ... ok
[INFO] [stdout] test resp::tests::test_deserialize_integer_thousand ... ok
[INFO] [stdout] test resp::tests::test_deserialize_simple_string_ok ... ok
[INFO] [stdout] test resp::tests::test_deserialize_simple_string_empty ... ok
[INFO] [stdout] test resp::tests::test_parse_len_int_parse_err ... ok
[INFO] [stdout] test resp::tests::test_deserialize_integer_zero ... ok
[INFO] [stdout] test resp::tests::test_parse_len_negative_garbage1 ... ok
[INFO] [stdout] test resp::tests::test_parse_len_negative_garbage2 ... ok
[INFO] [stdout] test resp::tests::test_parse_len_negative_one ... ok
[INFO] [stdout] test resp::tests::test_parse_len_negative_twelve ... ok
[INFO] [stdout] test resp::tests::test_parse_len_negative_two ... ok
[INFO] [stdout] test resp::tests::test_parse_len_123456 ... ok
[INFO] [stdout] test resp::tests::test_deserialize_array_with_null_elt ... ok
[INFO] [stdout] test cmd::tests::handle_ping_ping_with_arg ... ok
[INFO] [stdout] test resp::tests::test_deserialize_a_nested_array ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_02_px_get_on_time ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_03_px_get_expired ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_08_set_px_set_px_get_on_time_twice_then_expired ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_07_set_px_set_get_on_time_should_not_expire ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_06_set_set_px_get_on_time_then_expired ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_04_ex_get_on_time ... ok
[INFO] [stdout] test cmd::tests::handle_request_set_05_ex_get_expired ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.20s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/redis_server-2215ded481e98464)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests redis_server
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "5e1f236c4d2bd5a44e6c05a594253a5694f2cf18d82374f5fef057aa28706156", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5e1f236c4d2bd5a44e6c05a594253a5694f2cf18d82374f5fef057aa28706156", kill_on_drop: false }`
[INFO] [stdout] 5e1f236c4d2bd5a44e6c05a594253a5694f2cf18d82374f5fef057aa28706156
